[INFO] fetching crate iron_runtime_analytics 0.4.0...
[INFO] testing iron_runtime_analytics-0.4.0 against try#0abe69e6c16114311cc2700e972492e64d69c28f for pr-154065-1
[INFO] extracting crate iron_runtime_analytics 0.4.0 into /workspace/builds/worker-3-tc2/source
[INFO] started tweaking crates.io crate iron_runtime_analytics 0.4.0
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate iron_runtime_analytics 0.4.0
[INFO] tweaked toml for crates.io crate iron_runtime_analytics 0.4.0 written to /workspace/builds/worker-3-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate iron_runtime_analytics 0.4.0 on toolchain 0abe69e6c16114311cc2700e972492e64d69c28f
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate iron_runtime_analytics 0.4.0 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] [stderr]     Blocking waiting for file lock on package cache
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] c746d82e5834abd81bf90f92cdc1cef70732c8188202ea894caf6b1a6728d0da
[INFO] running `Command { std: "docker" "start" "-a" "c746d82e5834abd81bf90f92cdc1cef70732c8188202ea894caf6b1a6728d0da", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "c746d82e5834abd81bf90f92cdc1cef70732c8188202ea894caf6b1a6728d0da", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c746d82e5834abd81bf90f92cdc1cef70732c8188202ea894caf6b1a6728d0da", kill_on_drop: false }`
[INFO] [stdout] c746d82e5834abd81bf90f92cdc1cef70732c8188202ea894caf6b1a6728d0da
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 31333e216beaa5440beadefff40604fa6fd5f9629d24ae604e767a6c1162eb53
[INFO] running `Command { std: "docker" "start" "-a" "31333e216beaa5440beadefff40604fa6fd5f9629d24ae604e767a6c1162eb53", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.103
[INFO] [stderr]    Compiling quote v1.0.42
[INFO] [stderr]    Compiling libc v0.2.178
[INFO] [stderr]    Compiling unicode-ident v1.0.22
[INFO] [stderr]    Compiling cfg-if v1.0.4
[INFO] [stderr]    Compiling crossbeam-utils v0.8.21
[INFO] [stderr]    Compiling serde_core v1.0.228
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling scopeguard v1.2.0
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling lock_api v0.4.14
[INFO] [stderr]    Compiling pin-project-lite v0.2.16
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling tracing-core v0.1.35
[INFO] [stderr]    Compiling serde_json v1.0.145
[INFO] [stderr]    Compiling hashbrown v0.14.5
[INFO] [stderr]    Compiling memchr v2.7.6
[INFO] [stderr]    Compiling itoa v1.0.15
[INFO] [stderr]    Compiling bytes v1.11.0
[INFO] [stderr]    Compiling crossbeam-epoch v0.9.18
[INFO] [stderr]    Compiling ryu v1.0.20
[INFO] [stderr]    Compiling syn v2.0.111
[INFO] [stderr]    Compiling crossbeam-queue v0.3.12
[INFO] [stderr]    Compiling crossbeam-channel v0.5.15
[INFO] [stderr]    Compiling crossbeam-deque v0.8.6
[INFO] [stderr]    Compiling arc-swap v1.7.1
[INFO] [stderr]    Compiling socket2 v0.6.1
[INFO] [stderr]    Compiling signal-hook-registry v1.4.7
[INFO] [stderr]    Compiling mio v1.1.1
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling dashmap v5.5.3
[INFO] [stderr]    Compiling crossbeam v0.8.4
[INFO] [stderr]    Compiling uuid v1.19.0
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling tokio v1.48.0
[INFO] [stderr]    Compiling tracing v0.1.41
[INFO] [stderr]    Compiling iron_types v0.3.0
[INFO] [stderr]    Compiling iron_cost v0.3.0
[INFO] [stderr]    Compiling iron_runtime_analytics v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 40.55s
[INFO] running `Command { std: "docker" "inspect" "31333e216beaa5440beadefff40604fa6fd5f9629d24ae604e767a6c1162eb53", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "31333e216beaa5440beadefff40604fa6fd5f9629d24ae604e767a6c1162eb53", kill_on_drop: false }`
[INFO] [stdout] 31333e216beaa5440beadefff40604fa6fd5f9629d24ae604e767a6c1162eb53
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 13876f951c747c69685d63eba8c1c054be5e6b11da5086f2ca633894e598a3f2
[INFO] running `Command { std: "docker" "start" "-a" "13876f951c747c69685d63eba8c1c054be5e6b11da5086f2ca633894e598a3f2", kill_on_drop: false }`
[INFO] [stderr]    Compiling smallvec v1.15.1
[INFO] [stderr]    Compiling stable_deref_trait v1.2.1
[INFO] [stderr]    Compiling syn v2.0.111
[INFO] [stderr]    Compiling memchr v2.7.6
[INFO] [stderr]    Compiling futures-core v0.3.31
[INFO] [stderr]    Compiling futures-sink v0.3.31
[INFO] [stderr]    Compiling litemap v0.8.1
[INFO] [stderr]    Compiling writeable v0.6.2
[INFO] [stderr]    Compiling slab v0.4.11
[INFO] [stderr]    Compiling icu_normalizer_data v2.1.1
[INFO] [stderr]    Compiling icu_properties_data v2.1.2
[INFO] [stderr]    Compiling futures-channel v0.3.31
[INFO] [stderr]    Compiling http v1.4.0
[INFO] [stderr]    Compiling pin-utils v0.1.0
[INFO] [stderr]    Compiling parking_lot_core v0.9.12
[INFO] [stderr]    Compiling equivalent v1.0.2
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling httparse v1.10.1
[INFO] [stderr]    Compiling fnv v1.0.7
[INFO] [stderr]    Compiling futures-io v0.3.31
[INFO] [stderr]    Compiling parking_lot v0.12.5
[INFO] [stderr]    Compiling atomic-waker v1.1.2
[INFO] [stderr]    Compiling try-lock v0.2.5
[INFO] [stderr]    Compiling futures-task v0.3.31
[INFO] [stderr]    Compiling want v0.3.1
[INFO] [stderr]    Compiling serde_json v1.0.145
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling http-body v1.0.1
[INFO] [stderr]    Compiling regex-syntax v0.8.8
[INFO] [stderr]    Compiling httpdate v1.0.3
[INFO] [stderr]    Compiling utf8_iter v1.0.4
[INFO] [stderr]    Compiling indexmap v2.12.1
[INFO] [stderr]    Compiling percent-encoding v2.3.2
[INFO] [stderr]    Compiling dashmap v5.5.3
[INFO] [stderr]    Compiling form_urlencoded v1.2.2
[INFO] [stderr]    Compiling num_cpus v1.17.0
[INFO] [stderr]    Compiling lazy_static v1.5.0
[INFO] [stderr]    Compiling deadpool-runtime v0.1.4
[INFO] [stderr]    Compiling http-body-util v0.1.3
[INFO] [stderr]    Compiling base64 v0.22.1
[INFO] [stderr]    Compiling log v0.4.29
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling synstructure v0.13.2
[INFO] [stderr]    Compiling zerofrom-derive v0.1.6
[INFO] [stderr]    Compiling yoke-derive v0.8.1
[INFO] [stderr]    Compiling zerovec-derive v0.11.2
[INFO] [stderr]    Compiling displaydoc v0.2.5
[INFO] [stderr]    Compiling tokio-macros v2.6.0
[INFO] [stderr]    Compiling tracing-attributes v0.1.31
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling tokio v1.48.0
[INFO] [stderr]    Compiling futures-macro v0.3.31
[INFO] [stderr]    Compiling tracing v0.1.41
[INFO] [stderr]    Compiling zerofrom v0.1.6
[INFO] [stderr]    Compiling thiserror-impl v1.0.69
[INFO] [stderr]    Compiling yoke v0.8.1
[INFO] [stderr]    Compiling regex v1.12.2
[INFO] [stderr]    Compiling zerovec v0.11.5
[INFO] [stderr]    Compiling zerotrie v0.2.3
[INFO] [stderr]    Compiling futures-util v0.3.31
[INFO] [stderr]    Compiling tinystr v0.8.2
[INFO] [stderr]    Compiling potential_utf v0.1.4
[INFO] [stderr]    Compiling icu_locale_core v2.1.1
[INFO] [stderr]    Compiling icu_collections v2.1.1
[INFO] [stderr]    Compiling thiserror v1.0.69
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling icu_provider v2.1.1
[INFO] [stderr]    Compiling icu_normalizer v2.1.1
[INFO] [stderr]    Compiling icu_properties v2.1.2
[INFO] [stderr]    Compiling iron_types v0.3.0
[INFO] [stderr]    Compiling assert-json-diff v2.0.2
[INFO] [stderr]    Compiling idna_adapter v1.2.1
[INFO] [stderr]    Compiling idna v1.1.0
[INFO] [stderr]    Compiling futures-executor v0.3.31
[INFO] [stderr]    Compiling url v2.5.7
[INFO] [stderr]    Compiling futures v0.3.31
[INFO] [stderr]    Compiling tokio-util v0.7.17
[INFO] [stderr]    Compiling iron_cost v0.3.0
[INFO] [stderr]    Compiling deadpool v0.12.3
[INFO] [stderr]    Compiling iron_runtime_analytics v0.4.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling h2 v0.4.12
[INFO] [stderr]    Compiling hyper v1.8.1
[INFO] [stderr]    Compiling hyper-util v0.1.19
[INFO] [stderr]    Compiling wiremock v0.6.5
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 1m 12s
[INFO] running `Command { std: "docker" "inspect" "13876f951c747c69685d63eba8c1c054be5e6b11da5086f2ca633894e598a3f2", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "13876f951c747c69685d63eba8c1c054be5e6b11da5086f2ca633894e598a3f2", kill_on_drop: false }`
[INFO] [stdout] 13876f951c747c69685d63eba8c1c054be5e6b11da5086f2ca633894e598a3f2
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-3-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 55540752dbcca8e048f66e4bd364f2f11eaaf71e6cd0854cd101eeb57ac5b6c8
[INFO] running `Command { std: "docker" "start" "-a" "55540752dbcca8e048f66e4bd364f2f11eaaf71e6cd0854cd101eeb57ac5b6c8", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.25s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/iron_runtime_analytics-a3c7cffbcbd4b351)
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/concurrency_test.rs (/opt/rustwide/target/debug/deps/concurrency_test-9a18417ecffe9430)
[INFO] [stdout] 
[INFO] [stdout] running 11 tests
[INFO] [stdout] test test_concurrent_mark_synced ... ok
[INFO] [stdout] test test_concurrent_recording_10_threads ... ok
[INFO] [stdout] test test_atomic_counters_consistent_under_load ... ok
[INFO] [stdout] test test_per_model_stats_consistent_under_load ... ok
[INFO] [stdout] test test_concurrent_record_and_drain ... ok
[INFO] [stdout] test test_concurrent_record_and_read ... ok
[INFO] [stdout] test test_concurrent_recording_100_threads ... ok
[INFO] [stdout] test test_concurrent_streaming ... ok
[INFO] [stdout] test test_recording_throughput ... ok
[INFO] [stdout] test test_no_deadlock_under_heavy_load ... ok
[INFO] [stdout] test test_stats_retrieval_is_fast ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 11 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.24s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/event_store_test.rs (/opt/rustwide/target/debug/deps/event_store_test-9bb8d9e21d14d527)
[INFO] [stdout] 
[INFO] [stdout] running 23 tests
[INFO] [stdout] test test_buffer_bounded_by_capacity ... ok
[INFO] [stdout] test test_atomic_counters_track_all_events ... ok
[INFO] [stdout] test test_dropped_count_tracks_overflow ... ok
[INFO] [stdout] test test_event_store_new_creates_empty_store ... ok
[INFO] [stdout] test test_event_store_with_capacity_respects_size ... ok
[INFO] [stdout] test test_drain_all_removes_events ... ok
[INFO] [stdout] test test_dropped_count_starts_at_zero ... ok
[INFO] [stdout] test test_mark_synced_all_events ... ok
[INFO] [stdout] test test_no_drops_when_buffer_has_space ... ok
[INFO] [stdout] test test_mark_synced_updates_count ... ok
[INFO] [stdout] test test_record_budget_threshold_reached ... ok
[INFO] [stdout] test test_record_llm_request_completed ... ok
[INFO] [stdout] test test_record_multiple_events ... ok
[INFO] [stdout] test test_record_single_event_increments_count ... ok
[INFO] [stdout] test test_streaming_nonblocking_when_channel_full ... ok
[INFO] [stdout] test test_streaming_sends_all_events ... ok
[INFO] [stdout] test test_record_llm_request_failed ... ok
[INFO] [stdout] test test_snapshot_events_returns_copy ... ok
[INFO] [stdout] test test_unsynced_events_returns_only_unsynced ... ok
[INFO] [stdout] test test_with_streaming_creates_channel ... ok
[INFO] [stdout] test test_record_never_blocks ... ok
[INFO] [stdout] test test_new_events_are_unsynced ... ok
[INFO] [stdout] test test_event_store_default_capacity_is_10000 ... ok
[INFO] [stderr]      Running tests/helpers_test.rs (/opt/rustwide/target/debug/deps/helpers_test-97bbdf7bbbb14cbe)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 23 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.12s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 13 tests
[INFO] [stdout] test test_infer_provider_anthropic_case_insensitive ... ok
[INFO] [stdout] test test_infer_provider_anthropic_claude3 ... ok
[INFO] [stdout] test test_infer_provider_openai_chatgpt ... ok
[INFO] [stdout] test test_infer_provider_openai_gpt ... ok
[INFO] [stdout] test test_infer_provider_openai_reasoning ... ok
[INFO] [stdout] test test_infer_provider_unknown ... ok
[INFO] [stdout] test test_provider_as_str ... ok
[INFO] [stdout] test test_provider_default ... ok
[INFO] [stdout] test test_provider_display ... ok
[INFO] [stdout] test test_provider_parse ... ok
[INFO] [stdout] test test_provider_to_arc_str ... ok
[INFO] [stdout] test test_provider_from_str_conversion ... ok
[INFO] [stdout] test test_infer_provider_anthropic_legacy ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 13 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/protocol_012_test.rs (/opt/rustwide/target/debug/deps/protocol_012_test-cb484f8b989c0638)
[INFO] [stdout] 
[INFO] [stdout] running 14 tests
[INFO] [stdout] test test_cost_stored_in_microdollars ... ok
[INFO] [stdout] test test_endpoint_1_total_spending_fields ... ok
[INFO] [stdout] test test_endpoint_5_request_usage ... ok
[INFO] [stdout] test test_endpoint_2_spending_by_agent ... ok
[INFO] [stdout] test test_endpoint_6_token_usage ... ok
[INFO] [stdout] test test_endpoint_7_model_usage ... ok
[INFO] [stdout] test test_endpoint_4_spending_by_provider ... ok
[INFO] [stdout] test test_event_id_is_internal ... ok
[INFO] [stdout] test test_llm_request_completed_has_all_protocol_fields ... ok
[INFO] [stdout] test test_llm_request_failed_has_all_protocol_fields ... ok
[INFO] [stdout] test test_timestamp_in_milliseconds ... ok
[INFO] [stdout] test test_small_cost_precision ... ok
[INFO] [stdout] test test_optional_fields_can_be_none ... ok
[INFO] [stdout] test test_endpoint_8_avg_cost_per_request ... ok
[INFO] [stderr]      Running tests/recording_test.rs (/opt/rustwide/target/debug/deps/recording_test-d6e96ff6e6d1df87)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 14 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test test_record_budget_threshold_100_percent ... ok
[INFO] [stdout] test test_record_budget_threshold_basic ... ok
[INFO] [stdout] test test_record_llm_completed_infers_anthropic_provider ... ok
[INFO] [stdout] test test_record_budget_threshold_with_agent ... ok
[INFO] [stdout] test test_mixed_recording_types ... ok
[INFO] [stdout] test test_event_timestamps_are_populated ... ok
[INFO] [stdout] test test_event_ids_are_unique ... ok
[INFO] [stdout] test test_record_llm_completed_infers_openai_provider ... ok
[INFO] [stdout] test test_record_llm_completed_unknown_model_zero_cost ... ok
[INFO] [stdout] test test_record_llm_failed_with_error_details ... ok
[INFO] [stdout] test test_record_llm_failed_basic ... ok
[INFO] [stdout] test test_record_router_started ... ok
[INFO] [stdout] test test_record_llm_completed_with_provider_id ... ok
[INFO] [stdout] test test_record_router_stopped_empty_stats ... ok
[INFO] [stdout] test test_record_llm_completed_updates_by_provider_stats ... ok
[INFO] [stdout] test test_record_llm_completed_basic ... ok
[INFO] [stdout] test test_record_llm_completed_with_agent_id ... ok
[INFO] [stdout] test test_record_router_stopped_with_stats ... ok
[INFO] [stdout] test test_record_llm_completed_with_explicit_provider ... ok
[INFO] [stdout] test test_record_llm_completed_updates_by_model_stats ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.13s
[INFO] [stdout] 
[INFO] [stderr]      Running tests/stats_test.rs (/opt/rustwide/target/debug/deps/stats_test-7b24114711bb6ea9)
[INFO] [stdout] 
[INFO] [stdout] running 23 tests
[INFO] [stdout] test test_stats_are_consistent_snapshot ... ok
[INFO] [stdout] test test_avg_cost_per_request_no_requests ... ok
[INFO] [stdout] test test_avg_tokens_per_request ... ok
[INFO] [stdout] test test_avg_tokens_per_request_no_requests ... ok
[INFO] [stdout] test test_model_stats_cost_usd ... ok
[INFO] [stdout] test test_failed_requests_counter ... ok
[INFO] [stdout] test test_failed_requests_dont_add_tokens_or_cost ... ok
[INFO] [stdout] test test_stats_by_model_single_model ... ok
[INFO] [stdout] test test_stats_by_model_tracks_failed_requests ... ok
[INFO] [stdout] test test_stats_by_provider_multiple_providers ... ok
[INFO] [stdout] test test_stats_by_provider_single_provider ... ok
[INFO] [stdout] test test_success_rate_all_success ... ok
[INFO] [stdout] test test_success_rate_no_requests ... ok
[INFO] [stdout] test test_success_rate_with_failures ... ok
[INFO] [stdout] test test_total_cost_micros_counter ... ok
[INFO] [stdout] test test_total_cost_usd_conversion ... ok
[INFO] [stdout] test test_total_cost_usd_small_amounts ... ok
[INFO] [stdout] test test_total_input_tokens_counter ... ok
[INFO] [stdout] test test_total_output_tokens_counter ... ok
[INFO] [stdout] test test_total_requests_counter ... ok
[INFO] [stdout] test test_avg_cost_per_request_usd ... ok
[INFO] [stdout] test test_stats_by_model_multiple_models ... ok
[INFO] [stderr]      Running tests/sync_test.rs (/opt/rustwide/target/debug/deps/sync_test-6419715af6dbf0ca)
[INFO] [stdout] test test_total_tokens ... ok
[INFO] [stderr]    Doc-tests iron_runtime_analytics
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 23 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.04s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 0 tests
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 3 tests
[INFO] [stdout] test src/lib.rs - (line 41) ... ignored
[INFO] [stdout] test src/lib.rs - (line 66) ... ignored
[INFO] [stdout] test src/lib.rs - (line 86) ... ignored
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 0 passed; 0 failed; 3 ignored; 0 measured; 0 filtered out; finished in 0.00s
[INFO] [stdout] 
[INFO] running `Command { std: "docker" "inspect" "55540752dbcca8e048f66e4bd364f2f11eaaf71e6cd0854cd101eeb57ac5b6c8", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "55540752dbcca8e048f66e4bd364f2f11eaaf71e6cd0854cd101eeb57ac5b6c8", kill_on_drop: false }`
[INFO] [stdout] 55540752dbcca8e048f66e4bd364f2f11eaaf71e6cd0854cd101eeb57ac5b6c8
